View Issue Details

Jump to NotesJump to History
IDProjectCategoryView StatusDate SubmittedLast Update
0001723T99X171.00 SKB EagleSW Issuepublic2023-05-19 10:282023-07-27 12:57
Reporter(ALTech) JunGyu Kim Assigned To(ALTech) JunGyu Kim Due Date
PrioritynormalSeveritys4-minorReproducibilitysometimes
Status closedResolutionfixed 
Summary0001723: [Smart3][ATV12] Resolution was changed to 720p due to invalid EDID
DescriptionHi Kerwin,

During the Sleep <-> Wake up aging test in FW 15.537.44, an issue occurred where the resolution was set to 720p because the EDID value was 00000...000.
=======================================================================================
05-12 17:40:09.756 3542 3575 E MesonHwc: addSupportedConfig meet error mode (null edid, 69)
05-12 17:40:09.756 4766 4766 D Sha256Manager: Sha256Manage encoding called and Param: 1ca39628-4c2d-40ec-8641-d08db40f42ca20230512174009.755
05-12 17:40:09.756 3542 3575 V MesonHwc: Read display content type SUCCESS.
05-12 17:40:09.756 3810 3810 D AS.AudioService: setCloseCaptionEnd() volume :21, mAvrcpAbsVolSupported=false
05-12 17:40:09.756 3542 3575 I MesonHwc: hdr_preference (dolby_vision)
05-12 17:40:09.757 3542 3575 E MesonHwc: dolby vision driver is not ready
05-12 17:40:09.757 3584 3707 I APM_AudioPolicyManager: setStreamVolumeIndex: set_btv_media_volume stream: 3 index : 21 device: 1024 :
05-12 17:40:09.757 3584 3707 I APM_AudioPolicyManager: setStreamVolumeIndex: set_btv_media_volume mExtMute: 0, mExtCC: 0
05-12 17:40:09.757 3542 3575 D MesonHwc: dolby version:0, hlg:0, hdr10:0, hdr10+:0 max:0, avg:0, min:0
05-12 17:40:09.757 3584 3707 I APM_AudioPolicyManager: setStreamVolumeIndex: checkDevice : 1
05-12 17:40:09.757 3542 3575 V MesonHwc: Update EDID:0000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000
05-12 17:40:09.757 3584 3707 I APM_AudioPolicyManager: setStreamVolumeIndex: set_btv_media_volume stream : 3 volume_index : 21 gain : -13.380000
05-12 17:40:09.757 3584 3707 D BtvMediaVolumeControlLib: btvMediaPlayerVolumeControl signal, newVolume:21, -13.380000
05-12 17:40:09.757 3542 3575 E MesonHwc: readSysFs, open /sys/module/aml_media/parameters/hdmi_authenticated fail.
05-12 17:40:09.757 3584 3707 I APM_AudioPolicyManager: setStreamVolumeIndex: set_btv_media_volume end !!
05-12 17:40:09.757 3542 3575 D MesonHwc: ConnectorHdmi::update to 1
05-12 17:40:09.757 4766 6748 D OkHttp : --> GET https://agw.sk-iptv.com:8443/scs/v510/product/info?synopsis_type=01&ver=15.537.442-0000&swVersion=15.537.442&method=get&stb_hdcp=HDCP_V2_2&adult_flag=0&pid=413105497&userAgent=BFX-AT100&ptype=0&stb_security_level=4&stb_id=%7BC254BB01-72C4-11E9-A51A-61AC1B87CDDD%7D&verf_req_data=f0daff118efcbc36fd66d87a09ca6a867bc70f7f824cee6eb991f9a9c691417a1a27606db1c99fce51e10e6711fe11788d95a2f9d80237c7b6590e6fc813d6e96dec0d1457b9f1ac75aa823da73a9549c71de77840c8bff52894df9456880d2354680163c165c0422c269696f024de18&mac_address=ec%3A5c%3A68%3A1d%3Abc%3A13&eag_protocol=RTSP%2CHLS&req_date=2023-05-12_17%3A40%3A09&purchase_flag=1&if=IF-SCS-PRODUCT-UI510-001&cid=%7B15425B1C-5C8C-40E3-AA57-4DA1BACA7CF4%7D
05-12 17:40:09.759 0 0 I [ 838.913547@2]- vout: vout_ioctl: cmd_dir = 0x2, cmd_nr = 0x0
05-12 17:40:09.757 3542 3575 D MesonHwc: sysfs(/sys/class/amhdmitx/amhdmitx0/hpd_state) read int32_t (1)
05-12 17:40:09.758 3542 3575 I MesonHwc: readDisplayPhySize physical size (16 x 9)
05-12 17:40:09.758 3542 3575 I MesonHwc: add fraction display mode (720p60hz)
05-12 17:40:09.758 3542 3575 I MesonHwc: add non fraction display mode (720p60hz)
=======================================================================================

As a result of checking the log, I found the log that about 10 seconds before this symptom appeared, the "cable plugin" log was duplicated in the Kernel log.
=======================================================================================
[05/12, 17:39:57] [ 826.389015@3]- hdmitx: amhdmitx: cable plugin
[05/12, 17:39:57] [ 826.390828@3]- hdmitx: amhdmitx: cable plugin
[05/12, 17:39:57] [ 826.395054@3]- hdmitx: amhdmitx: cable plugin
[05/12, 17:39:57] [ 826.397277@3]- hdmitx: amhdmitx: cable plugin
[05/12, 17:39:57] [ 826.399066@0]h hdmitx: amhdmitx: cable plugin
=======================================================================================

I asked Amlogic first for an analysis, and below is the answer.
https://jira.skbroadband.com/browse/AMANDROIDS-104

1. "hdmitx: amhdmitx: cable plugin" is not a log from SOC. Please check from the manufacturer first.
2. At 20:30:37 it dispatches an event "hdmitx_hpd=1 0" but the EDID is not read. It seems abnormal hpd. Please remove the manufacturer's custom code and review.

Please check the attached log and see if there are any additional abnormalities.
As requested by Amlogic, is possible to support testing after removing the manufacturer's custom code?

Steps To Reproduce1. Home -> My -> "사용자 맞춤 설정" -> Set "시작화면" to "B tv 홈"
2. Enter Power key every 10 seconds
TagsNo tags attached.
Attach Tags

Users monitoring this issue

User List (ALTech) SY Yoon , (ALTech) Younkwang Jung , (SW) Jason Ling

Activities

(ALTech) JunGyu Kim

2023-05-19 10:28

developer  

20230515_SleepWakeUp_STB_5.zip (3,154,151 bytes)

(SW) Jerry Lin

2023-05-19 18:01

developer   ~0013188

Hi Kim.
I will modify the delay time to fix this issue.
When the test FW is ready.
Please help to verify it in your side.

Normal Case:
/////////// AML Code ====> from "store_phy 0" to "system: plugout" ====> 318.501043 - 318.447078 = 53.965 ms
[05/12, 17:11:19] [ 318.447078@3]- hdmitx: system: store_phy 0
[05/12, 17:11:19] [ 318.497380@0]h hdmitx: system: irq 80000004 0
[05/12, 17:11:19] [ 318.497457@0]- hdmitx: system: update rx hdr info 0
[05/12, 17:11:19] [ 318.501043@0]- hdmitx: system: plugout

////////////// FXN code ====> delay 60ms and get plugout , if plugout , then read EDID
[05/12, 17:11:19] [ 318.516265@3]- hdmitx: amhdmitx: cable plugout, set hdev->hpd_lock to 1
[05/12, 17:11:19] [ 318.516265@3]- hdmitx: system: read EDID


Failed Case:
//////////////// AML Code ====> from "store_phy 0" to "system: plugout " ====> 298.334517 - 298.217023 = 117. 496 ms
[05/12, 17:10:58] [ 298.217023@3]- hdmitx: system: store_phy 0
[05/12, 17:10:59] [ 298.232910@0]- is_reset=1
[05/12, 17:10:59] [ 298.233167@0]- vframe_rate_uevent: sent uevent FRAME_RATE_HINT=0
[05/12, 17:10:59] [ 298.236517@3]- use keep buffer keep frame!
[05/12, 17:10:59] [ 298.240016@3]- vf_keep_current_locked: keep video successful!
[05/12, 17:10:59] [ 298.246061@3]- video_vf_unreg_provider: vd1 used: true, vd2 used: false, keep_ret:1, black_out:0, cur_dispbuf:ffffff800a9bbbf8
[05/12, 17:10:59] [ 298.257166@3]d video first pts = 0
[05/12, 17:10:59] [ 298.260465@3]- VD1 AFBC 0x0.
[05/12, 17:10:59] [ 298.263306@3]- pattern detected = 0, pts_enter_pattern_cnt =1, pts_exit_pattern_cnt =0
                                [ 298.271543@0]h hdmitx: system: irq 4 0
[05/12, 17:10:59] [ 298.272609@3]- is_reset=1
[05/12, 17:10:59] [ 298.272646@3]- vdec_init, dev_name:ammvdec_h264, vdec_type=VDEC_TYPE_FRAME_BLOCK vdec ffffff800d578000 id = 0
[05/12, 17:10:59] [ 298.273605@3]- H264 sysinfo: 1920x1080 duration=3200, pts_outside=1
[05/12, 17:10:59] [ 298.273671@3]- [TEE], the fw (h264_multi) will be loaded.

///////////////// FXN code ====> delay 60ms and get plugout , but can not get plugout , so do not read EDID
[05/12, 17:10:59] [ 298.279693@2]- hdmitx: amhdmitx: cable plugin
[05/12, 17:10:59] [ 298.282229@2]- hdmitx: amhdmitx: cable plugin
[05/12, 17:10:59] [ 298.283977@1]- hdmitx: amhdmitx: cable plugin
[05/12, 17:10:59] [ 298.286025@1]- hdmitx: amhdmitx: cable plugin
[05/12, 17:10:59] [ 298.292282@1]d hdmitx: amhdmitx: cable plugin

[05/12, 17:10:59] [ 298.292282@1]d timestamp_apts_enable enable:0,
[05/12, 17:10:59] [ 298.308117@2]d timestamp_apts_enable enable:1,
[05/12, 17:10:59] [ 298.334479@0]- hdmitx: system: update rx hdr info 0
[05/12, 17:10:59] [ 298.334517@0]- hdmitx: system: plugout

jerry

(ALTech) JunGyu Kim

2023-05-22 08:24

developer   ~0013190

Hi Jerry,

Thank you for analysis.
Please share when the test FW is ready. I will test it.

Thank you.
Kim

(SW) Jerry Lin

2023-05-22 15:07

developer   ~0013201

Hi Kim,
Please download FW from ALT Server.
File path:
/release_by_fxn/temp_wfh/jerry/eagle/mantis_1723/SD/usb_bfx-at100_V15.537.47.zip

Jerry

(ALTech) JunGyu Kim

2023-05-24 09:53

developer   ~0013210

Hi Jerry,

I was tested it with your test FW, the "EDID is 000000" case is still occurring.
============================================================================
05-23 19:20:21.233 3466 3513 V MesonHwc: Update EDID:0000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000
05-23 19:20:21.233 3466 3513 E MesonHwc: readSysFs, open /sys/module/aml_media/parameters/hdmi_authenticated fail.
05-23 19:20:21.233 3466 3513 D MesonHwc: ConnectorHdmi::update to 1
05-23 19:20:21.233 3466 3513 D MesonHwc: sysfs(/sys/class/amhdmitx/amhdmitx0/hpd_state) read int32_t (0)
05-23 19:20:21.233 3466 3513 D MesonHwc: ConnectorHdmi::update to 0
05-23 19:20:21.233 3466 3513 D MesonHwc: sysfs(/sys/class/amhdmitx/amhdmitx0/hpd_state) read int32_t (0)
05-23 19:20:21.233 3466 3513 I MesonHwc: crtc(10) update with no connector
05-23 19:20:21.233 3466 3513 D MesonHwc: handleEvent DRM_EVENT_HDMITX_HOTPLUG 11 VS 11
05-23 19:20:21.233 3466 3513 D MesonHwc: On hot plug: [Plug in]
05-23 19:20:21.233 3466 3513 D MesonHwc: received Uevent: change@/devices/virtual/amhdmitx/amhdmitx0
05-23 19:20:21.233 3466 3513 D MesonHwc: received Uevent: ACTION=change
05-23 19:20:21.233 3466 3513 D MesonHwc: received Uevent: DEVPATH=/devices/virtual/amhdmitx/amhdmitx0
05-23 19:20:21.233 3466 3513 D MesonHwc: received Uevent: SUBSYSTEM=amhdmitx
05-23 19:20:21.233 3466 3513 D MesonHwc: received Uevent: hdmitx_audio=1
05-23 19:20:21.233 3466 3513 D MesonHwc: received Uevent: MAJOR=246
05-23 19:20:21.233 3466 3513 D MesonHwc: received Uevent: MINOR=0
05-23 19:20:21.234 3466 3513 D MesonHwc: received Uevent: DEVNAME=amhdmitx0
05-23 19:20:21.234 3466 3513 D MesonHwc: received Uevent: SEQNUM=6817
05-23 19:20:21.234 3466 3513 D MesonHwc: received Uevent: 815
05-23 19:20:21.234 3466 3513 D MesonHwc: received Uevent: R=100
05-23 19:20:21.234 3466 3513 D MesonHwc: received Uevent: DEVNAME=framerate_dev
05-23 19:20:21.234 3466 3513 D MesonHwc: received Uevent: SEQNUM=6797
05-23 19:20:21.234 3466 3513 D MesonHwc: received Uevent: 93
05-23 19:20:21.234 3466 3513 D MesonHwc: received Uevent: :3b"
============================================================================

I have verified the kernel log, at this time, the "cable plugin" message is not duplicated.
============================================================================
124698:[Tue May 23 19:19:39 2023] hdmitx: amhdmitx: cable plugin resume
125335:[Tue May 23 19:19:59 2023] hdmitx: amhdmitx: cable plugin resume
126305:[Tue May 23 19:20:20 2023] hdmitx: amhdmitx: cable plugin resume
127115:[Tue May 23 19:20:40 2023] hdmitx: amhdmitx: cable plugin resume
127742:[Tue May 23 19:21:00 2023] hdmitx: amhdmitx: cable plugin resume
128346:[Tue May 23 19:21:20 2023] hdmitx: amhdmitx: cable plugin resume
128967:[Tue May 23 19:21:41 2023] hdmitx: amhdmitx: cable plugin resume
============================================================================

I have attached logcat and kernel log. Please check it.

Thank you
Kim
20230524_15.537.47.zip (14,187,716 bytes)

(ALTech) JunGyu Kim

2023-05-24 15:38

developer   ~0013218

Hi Jerry,

I have attached additional log for another board that issue occurred.
Please refer this log.
============================================================================
jgkim@DESKTOP-OR16SMS:/mnt/c/Users/USER/Desktop/edid/BFX-AT100_20230524-131217$ grep -rni 'edid:000000'
logcat.log.0005:96331:05-24 16:10:15.122 3467 3497 V MesonHwc: Update EDID:0000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000
logcat.log.0006:80838:05-24 16:04:51.610 3467 3497 V MesonHwc: Update EDID:0000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000
logcat.log.0009:19449:05-24 15:47:58.513 3467 3497 V MesonHwc: Update EDID:0000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000
logcat.log.0009:37803:05-24 15:48:38.966 3467 3497 V MesonHwc: Update EDID:0000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000
logcat.log.0010:106370:05-24 15:46:57.898 3467 3497 V MesonHwc: Update EDID:0000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000
============================================================================

Thank you.
Kim
20230525_15.537.47_2.zip (149,045,385 bytes)

(ALTech) JunGyu Kim

2023-05-25 13:44

developer   ~0013231

Hi Jerry,

SKB is planning to start BMT from next Tuesday.
So this issue needs to be fixed ASAP.
Please let me know if there are any updates.

Thank you.
Kim

(SW) Jerry Lin

2023-05-25 14:57

developer   ~0013233

Hi Kim ,
Please share me your test script.

Thanks.

Jerry

(ALTech) JunGyu Kim

2023-05-25 15:48

developer   ~0013234

Hi Jerry,

I attached test script.

Thank you.
Kim
switching_sleep_on_off_10.zip (328 bytes)

(SW) Jerry Lin

2023-05-25 17:46

developer   ~0013235

Hi Kim,
I can not reproduce this problem on my TV.
Have you tried other TVs ?

And i found a rather strange problem, that is, When SMART3 wakeup from standby mode, it still receives a HDMI hotplug interrupt form TV.
This interrupt will clear EDID.

[2023-05-24 15:47:58] [ 9378.690035] hdmitx: amhdmitx: cable plugin resume <== SMART3 wakeup
[2023-05-24 15:47:58] [ 9378.693517] hdmitx: system: update physical size: 630 330
[2023-05-24 15:47:58] [ 9378.693526] hdmitx: hw: set audio
[2023-05-24 15:47:58] [ 9378.693530] hdmitx: hw: hdmitx tx_aud_src = 0
[2023-05-24 15:47:58] [ 9378.693543] hdmitx: fs = 3, cd = 4, tmds_clk = 0
[2023-05-24 15:47:58] [ 9378.693563] hdmitx: hw: aud_n_para = 6144
[2023-05-24 15:47:58] [ 9378.693572] hdmitx: hw: set channel status
[2023-05-24 15:47:58] [ 9378.693589] hdmitx: hw: [0x10e3] = 0x1f
[2023-05-24 15:47:58] [ 9378.693609] hdmitx: audio: Audio Type: PCM
[2023-05-24 15:47:58] [ 9378.693791] hdmitx: hdmitx_set_uevent[223] hdmitx_hpd=1 0
[2023-05-24 15:47:58] [ 9378.693851] hdmitx: hdmitx_set_uevent[223] hdmitx_audio=1 0
[2023-05-24 15:47:58] [ 9378.694796] vout: vout_ioctl: cmd_dir = 0x2, cmd_nr = 0x0
[2023-05-24 15:47:58] [ 9378.704960] vout: vout_ioctl: cmd_dir = 0x2, cmd_nr = 0x0

[2023-05-24 15:47:58] [ 9378.722327] hdmitx: system: irq 4 0 <== HDMI Hotplug interrupt from TV
[2023-05-24 15:47:58] [ 9378.722430] hdmitx: system: update rx hdr info 7
[2023-05-24 15:47:58] [ 9378.722433] hdmitx: system: plugout
[2023-05-24 15:47:58] [ 9378.722437] hdmitx: hdmitx_set_drm_pkt: disable drm pkt
[2023-05-24 15:47:58] [ 9378.722450] hdmitx: hdmitx_set_hdr10plus_pkt: null vsif
[2023-05-24 15:47:58] [ 9378.722481] hdmitx: system: update physical size: 16 9
[2023-05-24 15:47:58] [ 9378.722637] hdmitx: hdmitx_set_uevent[223] hdmitx_hpd=0 0
[2023-05-24 15:47:58] [ 9378.722683] hdmitx: hdmitx_set_uevent[223] hdmitx_audio=0 0
[2023-05-24 15:47:58] [ 9378.755702] hdmitx: system: sname = invalid
[2023-05-24 15:47:58] [ 9378.755710] hdmitx: system: char_clk = 0
[2023-05-24 15:47:58] [ 9378.755713] hdmitx: system: cd = 4
[2023-05-24 15:47:58] [ 9378.755716] hdmitx: system: cs = 0
[2023-05-24 15:47:58] [ 9378.758588] cectx ff80023c.aocec: clear all logical addr 0
[2023-05-24 15:47:58] [ 9378.760297] cectx ff80023c.aocec: clear all logical addr 0
[2023-05-24 15:47:58] [ 9378.764389] cectx ff80023c.aocec: clear all logical addr 0
[2023-05-24 15:47:58] [ 9378.792147] ceca: tx len: 1 data: 44
[2023-05-24 15:47:58] [ 9378.818516] hdmitx: store_avmute 1
[2023-05-24 15:47:58] [ 9378.818527] hdmitx: hw: avmute set to 2
[2023-05-24 15:47:58] [ 9378.821277] hdmitx: system: set hdcp_pwr 1
[2023-05-24 15:47:58] [ 9378.867607] hdmitx: system: restore hdcp_pwr 0
[2023-05-24 15:47:58] [ 9378.867718] amhdmitx amhdmitx0: hdmitx20: stop14
[2023-05-24 15:47:58] [ 9378.867839] amhdmitx amhdmitx0: hdmitx20: stop22
[2023-05-24 15:47:58] [ 9378.895368] vout: vmode set to 576cvbs

Jerry

(ALTech) JunGyu Kim

2023-05-25 18:20

developer   ~0013237

Hi Jerry,

1. I tested it on several TVs (4K TV, monitor, etc..), and the symptom occurred in all of them.
2. The aging time when this issue occurred is at least 1~2 days. Please test in a long time.
3. Since the TV I tested did not have CEC, the TV did not turn off even when the STB entered sleep mode.
    Could an interrupt occur because the TV is not turned off?

Thank you.
Kim

(SW) Jerry Lin

2023-05-26 16:29

developer   ~0013248

Hi Kim,
I add a time check function for HDMI pulg event.
Please help to verify the test F/W on your side.
I wll test this weekend.

FW link:
/release_by_fxn/temp_wfh/jerry/eagle/mantis_1723/SD/0526/usb_bfx-at100_V15.537.47.zip

Jerry

(SW) Jerry Lin

2023-05-29 11:09

developer   ~0013252

Hi Kim ,
I checked my test report this morinig.
I grep "EDID:0000" in logcat file.
But i can not find any "EDID:0000" in my logcat file.

Jerry

(SW) Jerry Lin

2023-05-29 11:12

developer   ~0013253

EDID1 (26,220,016 bytes)

(ALTech) JunGyu Kim

2023-05-31 10:19

developer   ~0013267

Hi Jerry,

I tested in your test FW, the issue is still occurring.
===========================================================
05-30 23:30:28.365 29331 29338 E MesonHwc: addSupportedConfig meet error mode (null edid, 69)
05-30 23:30:28.365 29331 29338 V MesonHwc: Read display content type SUCCESS.
05-30 23:30:28.366 29331 29338 I MesonHwc: hdr_preference (dolby_vision)
05-30 23:30:28.366 29331 29338 E MesonHwc: dolby vision driver is not ready
05-30 23:30:28.366 29331 29338 D MesonHwc: dolby version:0, hlg:0, hdr10:0, hdr10+:0 max:0, avg:0, min:0
05-30 23:30:28.366 29331 29338 V MesonHwc: Update EDID:0000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000
===========================================================

The "cable plugin" event is still duplicated.
===========================================================
[2023-05-30 23:29:54] [48626.540265] hdmitx: amhdmitx: cable plugin
[2023-05-30 23:29:54] [48626.542296] hdmitx: amhdmitx: cable plugin
[2023-05-30 23:29:54] [48626.544664] hdmitx: amhdmitx: cable plugin
[2023-05-30 23:29:54] [48626.546691] hdmitx: amhdmitx: cable plugin
[2023-05-30 23:29:54] [48626.548649] hdmitx: amhdmitx: cable plugin
[2023-05-30 23:29:54] [48626.550707] hdmitx: amhdmitx: hdmi reset event happened
[2023-05-30 23:29:54] [48626.550713] hdmitx: amhdmitx: cable plugin
[2023-05-30 23:29:54] [48626.568230] hdmitx: amhdmitx: cable plugin
[2023-05-30 23:29:54] [48626.588255] hdmitx: amhdmitx: cable plugin
[2023-05-30 23:29:54] [48626.607238] hdmitx: amhdmitx: cable plugin
===========================================================


You said it couldn't be reproduced, but please check if the settings below are set.
Home -> My -> "사용자 맞춤 설정" -> Set "시작화면" to "B tv 홈"

Thank you.
Kim

(ALTech) JunGyu Kim

2023-05-31 10:20

developer   ~0013268

Hi Jerry,

I tested in your test FW, the issue is still occurring.
===========================================================
05-30 23:30:28.365 29331 29338 E MesonHwc: addSupportedConfig meet error mode (null edid, 69)
05-30 23:30:28.365 29331 29338 V MesonHwc: Read display content type SUCCESS.
05-30 23:30:28.366 29331 29338 I MesonHwc: hdr_preference (dolby_vision)
05-30 23:30:28.366 29331 29338 E MesonHwc: dolby vision driver is not ready
05-30 23:30:28.366 29331 29338 D MesonHwc: dolby version:0, hlg:0, hdr10:0, hdr10+:0 max:0, avg:0, min:0
05-30 23:30:28.366 29331 29338 V MesonHwc: Update EDID:0000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000
===========================================================

The "cable plugin" event is still duplicated.
===========================================================
[2023-05-30 23:29:54] [48626.540265] hdmitx: amhdmitx: cable plugin
[2023-05-30 23:29:54] [48626.542296] hdmitx: amhdmitx: cable plugin
[2023-05-30 23:29:54] [48626.544664] hdmitx: amhdmitx: cable plugin
[2023-05-30 23:29:54] [48626.546691] hdmitx: amhdmitx: cable plugin
[2023-05-30 23:29:54] [48626.548649] hdmitx: amhdmitx: cable plugin
[2023-05-30 23:29:54] [48626.550707] hdmitx: amhdmitx: hdmi reset event happened
[2023-05-30 23:29:54] [48626.550713] hdmitx: amhdmitx: cable plugin
[2023-05-30 23:29:54] [48626.568230] hdmitx: amhdmitx: cable plugin
[2023-05-30 23:29:54] [48626.588255] hdmitx: amhdmitx: cable plugin
[2023-05-30 23:29:54] [48626.607238] hdmitx: amhdmitx: cable plugin
===========================================================


You said it couldn't be reproduced, but please check if the settings below are set.
Home -> My -> "사용자 맞춤 설정" -> Set "시작화면" to "B tv 홈"

Thank you.
Kim
20230531_log.7z (251,192,772 bytes)

(ALTech) JunGyu Kim

2023-06-02 16:48

developer   ~0013285

Last edited: 2023-06-02 16:49

 Hi Jerry,

Today, I received a request from Amlogic Korea for the location of the code that causes this issue, and I shared the location where the "cable plugin" is output.
Amlogic engineer reviewed the commit of the fix, and they comments on the fix as follows.

======================================================================
123 + hdmitx_wr_reg(HDMITX_TOP_INTR_STAT, 0x80000004); // this will force the HPD fall interrupt and kernel will run bottom of plugout_handler

127 + if (get_hpd_state() == 1){ //plugin
128 + pr_info("amhdmitx: cable plugin");
129 + usleep_range(1000, 2000);
130 + }else {
131 + pr_info("amhdmitx: cable plugout, set hdev->hpd_lock to 1");
132 +
133 + if (hdmitx_hpd_hw_op(HPD_READ_HPD_GPIO)){ // suppose the HPD is high
134 + pr_info(SYS "read EDID\n");
135 + if (hdev->chip_type >= MESON_CPU_ID_G12A)
136 + hdev->hwop.cntlmisc(hdev,MISC_I2C_RESET, 0);
137 + /* start reading E-EDID */
138 + if (hdev->repeater_tx) rx_repeat_hpd_state(1);
139 + hdmitx_get_edid(hdev); // here will read/parse edid, but may in race condition with bottom of plugout_handler
140 + }

this patch seems fix some coding style, but no necessary code change
setclk_mutex // suggest this mutex lock/unlock in the enter / exit of this function to avoid race
actually, this function is containing two parts
one is buf[0] == '1' // suspend
another is buf[0] == '0'
I means that the things in suspend or in resume should be mutex
======================================================================

Please check Amlogic's comment.
If you need to get more information, you can check the latest comment of below jira page and you can also contact directly through this jira.
https://jira.skbroadband.com/browse/AMANDROIDS-104

Thank you.
Kim
image-2023-06-02-17-12-18-688.png (279,020 bytes)

(ALTech) Younkwang Jung

2023-06-08 08:23

developer   ~0013309

Hi Jerry

SKB is requesting an update on the progress
Please let me know the progress.

Thank you
YK.Jung

(ALTech) JunGyu Kim

2023-06-12 09:18

developer   ~0013328

Hi Jerry,

Please update the progress of this issue.

Thank you.
Kim

(SW) Jerry Lin

2023-06-12 11:07

developer   ~0013331

Hi Kim,
I confirm the method you privoded.
I will modify the mutex lock and EDID method.

Jerry

(SW) Jerry Lin

2023-06-16 10:06

developer   ~0013403

Hi Kim,
I add a mutex lock for HDMI pulg event.
Please help to verify the test F/W on your side.
I had a test last night, but i still can't reproduce the problem in my side.
I wll test this weekend.

FW link:
/release_by_fxn/temp_wfh/jerry/eagle/mantis_1723/SD/0616/usb_bfx-at100_V15.537.53.zip

Jerry

(ALTech) JunGyu Kim

2023-06-20 10:29

developer   ~0013460

Hi Jerry,

I have tested while this weekend, "EDID is 00000" case was occurred.
I attached logcat and kernel log.
Please check it.

Thank you.
Kim
20230620_log.zip (97,900,437 bytes)

(SW) Jerry Lin

2023-06-20 11:45

developer   ~0013463

Hi Kim,
I have question about your test environment.
I check with the time_use file.
The time_use file is
1. set start time for hdmi resume
2. set end time for hdmi plugout event

Time point:
[2023-06-18 21:27:14] [180229.799942@0]- hdmitx: system: time_use: 10716ms
[2023-06-18 21:27:29] [180249.940834@0]- hdmitx: system: time_use: 10504ms
[2023-06-18 21:27:49] [180270.080845@0]- hdmitx: system: time_use: 10434ms
[2023-06-18 21:28:09] [180290.348158@0]- hdmitx: system: time_use: 10444ms
[2023-06-18 21:28:29] [180310.543671@0]- hdmitx: system: time_use: 10433ms
[2023-06-18 21:29:00] [180341.057988@0]- hdmitx: system: time_use: 10616ms
[2023-06-18 21:29:20] [180361.090625@0]- hdmitx: system: time_use: 10450ms

Has the environment changed before and after this time point?
After this time point , the vaule of time_use is very close to 10 seconds. as in my tests.
Jerry
time_use (1,427,498 bytes)

(ALTech) JunGyu Kim

2023-06-20 12:45

developer   ~0013464

Hi Jerry,

At that time, there are no environment change. I found that the tombstone was generated at this time.
This issue is know issue. Already assigned to Amlogic.

What I've checked,the "EDID is 000000" case is occurring before.
========================================================================
06-16 23:13:18.279 3429 3523 D SystemControl: [CPQControl]:CheckOutPutMode: size is 7, str is : dum!
06-16 23:13:18.279 3429 3523 D SystemControl: [CPQControl]:CheckOutPutMode: inputFrameHeight: 1080, outputFrameHeight: 0!
06-16 23:13:18.279 3429 3523 D SystemControl: [CPQControl]:CheckOutPutMode: output mode is 13!
06-16 23:13:18.279 3429 3523 D SystemControl: [CPQControl]:SetCurrentSourceInputInfo: same signal, no need set!
06-16 23:13:18.280 3429 3470 I SystemControl: [/HDCPTxAuth.cpp, removeEdidXmlFile, 660] removeSKBEdidFile
06-16 23:13:18.284 3429 3470 I SystemControl: [/UEventObserver.cpp, isMatch_5_4, 147] Matched uevent message with pattern: change@/devices/virtual/amhdmitx/amhdmitx0
06-16 23:13:18.284 3429 3470 I SystemControl: [/HDCPTxAuth.cpp, TxUenventThreadLoop_5_4, 1340] HDMI TX switch_name:hdmitx_audio, switch_state: 0
06-16 23:13:18.284 3429 3470 D SystemControl: [/DisplayMode.cpp, onTxEvent, 3443] onTxEvent switchName:hdmitx_audio hpdstate:0 state: 1
06-16 23:13:18.284 3429 3470 I SystemControl: [/SystemControlHal.cpp, onEvent, 74] onEvent event:4, client size:1
06-16 23:13:18.284 3461 3495 D MesonHwc: dolby version:0, hlg:0, hdr10:0, hdr10+:0 max:0, avg:0, min:0
06-16 23:13:18.285 3461 3495 V MesonHwc: Update EDID:0000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000
06-16 23:13:18.285 3429 3470 I SystemControl: [/UEventObserver.cpp, isMatch_5_4, 147] Matched uevent message with pattern: change@/devices/virtual/amhdmitx/amhdmitx0
06-16 23:13:18.285 3429 3470 I SystemControl: [/HDCPTxAuth.cpp, TxUenventThreadLoop_5_4, 1340] HDMI TX switch_name:hdmitx_hdcp, switch_state: 0
========================================================================

Thank you.
Kim
tombstone_08 (401,524 bytes)

(ALTech) JunGyu Kim

2023-06-26 15:12

developer   ~0013499

Hi Jerry,

Please update the progress of this issue.
Thank you.
Kim

(SW) Jerry Lin

2023-06-29 15:59

developer   ~0013531

Hi Kim,
I will share you test FW tomorrow.
And i add a function to avoid clearing edid.
If the HDMI cable is connected.

Jerry

(ALTech) JunGyu Kim

2023-07-03 09:29

developer   ~0013540

Hi Jerry,

When can I get the test FW?

Thank you.
Kim

(SW) Jerry Lin

2023-07-03 12:09

developer   ~0013548

Hi Kim,
I add a function to avoid clearing edid.
Please help to verify the test F/W on your side.

FW link:
/release_by_fxn/temp_wfh/jerry/eagle/mantis_1723/SD/0703/usb_bfx-at100_V15.537.55.zip

Jerry

(ALTech) JunGyu Kim

2023-07-12 19:10

developer   ~0013620

Hi Jerry,

I tested your test FW, EDID 000000 case is still occurring.
Please check attached log.

=================================================================
BFX-AT100_20230703-170135/logcat.log.0070:14532:07-04 01:01:08.037 3521 3553 V MesonHwc: Update EDID:0000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000
=================================================================

Thank you.
Kim
BFX-AT100_20230703-170135.7z (137,684,317 bytes)

(SW) Jerry Lin

2023-07-26 16:28

developer   ~0013735

Hi Kim ,
I check the log that you provided.
I found that the HPD value was incorrect , so the EDID value was cleared.
Because the HDMI cable is connected all the time, the HPD value should be true,
Can you help to confirm with AML about this issue?
     
Normal Case:
07-04 01:01:16.895 0 0 I [28941.251672@0]- hdmitx: system: plugout
07-04 01:01:16.895 0 0 I [28941.255222@0]d hdmitx: hdmitx_set_drm_pkt: disable drm pkt
07-04 01:01:16.911 0 0 I [28941.260866@0]d hdmitx: TV not support DV, clr dv_vsif
07-04 01:01:16.912 0 0 I [28941.265574@0]d hdmitx: hdmitx: H14b VSIF, switching signal to SDR
07-04 01:01:16.922 0 0 I [28941.272264@0]- hdmitx: hdmitx_set_hdr10plus_pkt: null vsif
07-04 01:01:16.922 0 0 I [28941.277230@0]- hdmitx: system: update physical size: 16 9
07-04 01:01:16.922 0 0 I [28941.282554@0]- hdmitx: system: Do not clear EDID in plugout , hdmi cable connect <== Here
07-04 01:01:16.936 0 0 I [28941.290415@0]- hdmitx: hdmitx_set_uevent[226] hdmitx_hpd=0 0
..
.


Failed Case:
07-04 01:01:08.178 0 0 I [28932.392203@0]- hdmitx: system: plugout
07-04 01:01:08.178 0 0 I [28932.392208@0]d hdmitx: hdmitx_set_drm_pkt: disable drm pkt
07-04 01:01:08.178 0 0 I [28932.392223@0]d hdmitx: TV not support DV, clr dv_vsif
07-04 01:01:08.178 0 0 I [28932.392239@0]d hdmitx: hdmitx: H14b VSIF, switching signal to SDR
07-04 01:01:08.178 0 0 I [28932.392263@0]- hdmitx: hdmitx_set_hdr10plus_pkt: null vsif
07-04 01:01:08.178 0 0 I [28932.392296@0]- hdmitx: system: update physical size: 16 9
07-04 01:01:08.178 0 0 I [28932.392485@0]- hdmitx: hdmitx_set_uevent[226] hdmitx_hpd=0 0
.
.
07-04 01:01:08.037 3521 3553 V MesonHwc: Update EDID:0000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000


My modify code in common/drivers/amlogic/media/vout/hdmitx/hdmi_tx_20/hdmi_tx_main.c
static void hdmitx_hpd_plugout_handler(struct work_struct *work)
{
.
. /// Foxconn JERRY add for test //////
        if (hdmitx_hpd_hw_op(HPD_READ_HPD_GPIO))
                pr_info(SYS "Do not clear EDID in plugout , hdmi cable connect\n");
        else{
                hdmitx_edid_ram_buffer_clear(hdev);
        }
.
.
}

Jerry

(ALTech) JunGyu Kim

2023-07-27 12:56

developer   ~0013738

Hi Jerry,

As a result of internal discussion, it was decided to close this issue.
When this issue first occurred, it was discussed as an issue because a black screen occurred when changing the 720p resolution.
Currently, when set to 720p, it changes normally, and since recovery is possible.

If this issue causes any other issues, I'll let you know. I'll also ask Amlogic.
Thank you for support.

Kim

Issue History

Date Modified Username Field Change
2023-05-19 10:28 (ALTech) JunGyu Kim New Issue
2023-05-19 10:28 (ALTech) JunGyu Kim Status new => assigned
2023-05-19 10:28 (ALTech) JunGyu Kim Assigned To => (SW) Kerwin Chen
2023-05-19 10:28 (ALTech) JunGyu Kim File Added: 20230515_SleepWakeUp_STB_5.zip
2023-05-19 10:28 (ALTech) JunGyu Kim Issue Monitored: (ALTech) SY Yoon
2023-05-19 10:28 (ALTech) JunGyu Kim Issue Monitored: (ALTech) Younkwang Jung
2023-05-19 11:31 (SW) Kerwin Chen Assigned To (SW) Kerwin Chen => (SW) Jerry Lin
2023-05-19 18:01 (SW) Jerry Lin Note Added: 0013188
2023-05-22 08:24 (ALTech) JunGyu Kim Note Added: 0013190
2023-05-22 15:07 (SW) Jerry Lin Note Added: 0013201
2023-05-24 09:53 (ALTech) JunGyu Kim Note Added: 0013210
2023-05-24 09:53 (ALTech) JunGyu Kim File Added: 20230524_15.537.47.zip
2023-05-24 15:38 (ALTech) JunGyu Kim Note Added: 0013218
2023-05-24 15:38 (ALTech) JunGyu Kim File Added: 20230525_15.537.47_2.zip
2023-05-25 13:44 (ALTech) JunGyu Kim Note Added: 0013231
2023-05-25 14:57 (SW) Jerry Lin Note Added: 0013233
2023-05-25 15:48 (ALTech) JunGyu Kim Note Added: 0013234
2023-05-25 15:48 (ALTech) JunGyu Kim File Added: switching_sleep_on_off_10.zip
2023-05-25 17:46 (SW) Jerry Lin Note Added: 0013235
2023-05-25 18:20 (ALTech) JunGyu Kim Note Added: 0013237
2023-05-26 16:29 (SW) Jerry Lin Note Added: 0013248
2023-05-29 11:09 (SW) Jerry Lin Note Added: 0013252
2023-05-29 11:12 (SW) Jerry Lin Note Added: 0013253
2023-05-29 11:12 (SW) Jerry Lin File Added: EDID1
2023-05-31 10:19 (ALTech) JunGyu Kim Note Added: 0013267
2023-05-31 10:20 (ALTech) JunGyu Kim Note Added: 0013268
2023-05-31 10:20 (ALTech) JunGyu Kim File Added: 20230531_log.7z
2023-06-02 16:48 (ALTech) JunGyu Kim Note Added: 0013285
2023-06-02 16:48 (ALTech) JunGyu Kim File Added: image-2023-06-02-17-12-18-688.png
2023-06-02 16:49 (ALTech) JunGyu Kim Note Edited: 0013285
2023-06-08 08:23 (ALTech) Younkwang Jung Note Added: 0013309
2023-06-12 09:18 (ALTech) JunGyu Kim Note Added: 0013328
2023-06-12 11:07 (SW) Jerry Lin Note Added: 0013331
2023-06-16 10:06 (SW) Jerry Lin Note Added: 0013403
2023-06-20 10:29 (ALTech) JunGyu Kim Note Added: 0013460
2023-06-20 10:29 (ALTech) JunGyu Kim File Added: 20230620_log.zip
2023-06-20 11:45 (SW) Jerry Lin Note Added: 0013463
2023-06-20 11:45 (SW) Jerry Lin File Added: time_use
2023-06-20 12:45 (ALTech) JunGyu Kim Note Added: 0013464
2023-06-20 12:45 (ALTech) JunGyu Kim File Added: tombstone_08
2023-06-20 15:06 (SW) Jason Ling Issue Monitored: (SW) Jason Ling
2023-06-26 15:12 (ALTech) JunGyu Kim Note Added: 0013499
2023-06-29 15:59 (SW) Jerry Lin Note Added: 0013531
2023-07-03 09:29 (ALTech) JunGyu Kim Note Added: 0013540
2023-07-03 12:09 (SW) Jerry Lin Note Added: 0013548
2023-07-07 17:46 (SW) Jason Ling Assigned To (SW) Jerry Lin => (ALTech) JW Kim
2023-07-07 17:46 (SW) Jason Ling Assigned To (ALTech) JW Kim => (ALTech) JunGyu Kim
2023-07-12 19:10 (ALTech) JunGyu Kim Note Added: 0013620
2023-07-12 19:10 (ALTech) JunGyu Kim File Added: BFX-AT100_20230703-170135.7z
2023-07-26 16:28 (SW) Jerry Lin Note Added: 0013735
2023-07-27 12:56 (ALTech) JunGyu Kim Note Added: 0013738
2023-07-27 12:57 (ALTech) JunGyu Kim Status assigned => closed
2023-07-27 12:57 (ALTech) JunGyu Kim Resolution open => fixed